[INFO] fetching crate rustledger-booking 0.10.1...
[INFO] testing rustledger-booking-0.10.1 against master#1f7f8ea0721a3b1eb73e6c6d25cccb371434b320 for pr-154065-1
[INFO] extracting crate rustledger-booking 0.10.1 into /workspace/builds/worker-6-tc1/source
[INFO] started tweaking crates.io crate rustledger-booking 0.10.1
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate rustledger-booking 0.10.1
[INFO] tweaked toml for crates.io crate rustledger-booking 0.10.1 written to /workspace/builds/worker-6-tc1/source/Cargo.toml
[INFO] validating manifest of crates.io crate rustledger-booking 0.10.1 on toolchain 1f7f8ea0721a3b1eb73e6c6d25cccb371434b320
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate rustledger-booking 0.10.1 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]  Downloading crates ...
[INFO] [stderr]   Downloaded bigdecimal v0.4.10
[INFO] [stderr]   Downloaded rustledger-core v0.10.0
[INFO] [stderr]   Downloaded toml_edit v0.25.4+spec-1.1.0
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 8f5b4f38d2dffc5e28dccecad921d429a036a7ae643dd15fb7792d06b5306344
[INFO] running `Command { std: "docker" "start" "-a" "8f5b4f38d2dffc5e28dccecad921d429a036a7ae643dd15fb7792d06b5306344", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "8f5b4f38d2dffc5e28dccecad921d429a036a7ae643dd15fb7792d06b5306344", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8f5b4f38d2dffc5e28dccecad921d429a036a7ae643dd15fb7792d06b5306344", kill_on_drop: false }`
[INFO] [stdout] 8f5b4f38d2dffc5e28dccecad921d429a036a7ae643dd15fb7792d06b5306344
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] de7a5e1369714d4244822fa493289004b206abf2dfa360ad72925faf6dca7938
[INFO] running `Command { std: "docker" "start" "-a" "de7a5e1369714d4244822fa493289004b206abf2dfa360ad72925faf6dca7938", kill_on_drop: false }`
[INFO] [stderr]    Compiling simdutf8 v0.1.5
[INFO] [stderr]    Compiling rust_decimal v1.40.0
[INFO] [stderr]    Compiling bigdecimal v0.4.10
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling ptr_meta_derive v0.3.1
[INFO] [stderr]    Compiling bytecheck_derive v0.8.2
[INFO] [stderr]    Compiling munge_macro v0.4.7
[INFO] [stderr]    Compiling rkyv_derive v0.8.15
[INFO] [stderr]    Compiling rust_decimal_macros v1.40.0
[INFO] [stderr]    Compiling thiserror v2.0.18
[INFO] [stderr]    Compiling chrono v0.4.44
[INFO] [stderr]    Compiling ptr_meta v0.3.1
[INFO] [stderr]    Compiling munge v0.4.7
[INFO] [stderr]    Compiling rancor v0.1.1
[INFO] [stderr]    Compiling bytecheck v0.8.2
[INFO] [stderr]    Compiling rend v0.5.3
[INFO] [stderr]    Compiling rkyv v0.8.15
[INFO] [stderr]    Compiling rustledger-core v0.10.0
[INFO] [stderr]    Compiling rustledger-booking v0.10.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 16.93s
[INFO] running `Command { std: "docker" "inspect" "de7a5e1369714d4244822fa493289004b206abf2dfa360ad72925faf6dca7938", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "de7a5e1369714d4244822fa493289004b206abf2dfa360ad72925faf6dca7938", kill_on_drop: false }`
[INFO] [stdout] de7a5e1369714d4244822fa493289004b206abf2dfa360ad72925faf6dca7938
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] e99f1a97ee81637126b5ddd04127573bbd17c493d36ad23430c4a0aeb5e715b4
[INFO] running `Command { std: "docker" "start" "-a" "e99f1a97ee81637126b5ddd04127573bbd17c493d36ad23430c4a0aeb5e715b4", kill_on_drop: false }`
[INFO] [stderr]    Compiling zerocopy v0.8.42
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling wait-timeout v0.2.1
[INFO] [stderr]    Compiling bit-vec v0.8.0
[INFO] [stderr]    Compiling tempfile v3.26.0
[INFO] [stderr]    Compiling rand_core v0.9.5
[INFO] [stderr]    Compiling bit-set v0.8.0
[INFO] [stderr]    Compiling rusty-fork v0.3.1
[INFO] [stderr]    Compiling rand_xorshift v0.4.0
[INFO] [stderr]    Compiling rand v0.9.2
[INFO] [stderr]    Compiling ppv-lite86 v0.2.21
[INFO] [stderr]    Compiling rand_chacha v0.9.0
[INFO] [stderr]    Compiling proptest v1.10.0
[INFO] [stderr]    Compiling rustledger-booking v0.10.1 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 13.03s
[INFO] running `Command { std: "docker" "inspect" "e99f1a97ee81637126b5ddd04127573bbd17c493d36ad23430c4a0aeb5e715b4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e99f1a97ee81637126b5ddd04127573bbd17c493d36ad23430c4a0aeb5e715b4", kill_on_drop: false }`
[INFO] [stdout] e99f1a97ee81637126b5ddd04127573bbd17c493d36ad23430c4a0aeb5e715b4
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-6-tc1/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+1f7f8ea0721a3b1eb73e6c6d25cccb371434b320" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 2df29c083682d2cadbf753feccafb4e01ce15cc9c16db3ff3ce578769e9723da
[INFO] running `Command { std: "docker" "start" "-a" "2df29c083682d2cadbf753feccafb4e01ce15cc9c16db3ff3ce578769e9723da", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.11s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/rustledger_booking-aef364692170b47d)
[INFO] [stdout] 
[INFO] [stdout] running 74 tests
[INFO] [stdout] test book::tests::test_book_augmentation_not_reduction ... ok
[INFO] [stdout] test book::tests::test_book_no_inventory_for_account ... ok
[INFO] [stdout] test book::tests::test_book_no_cost_specs_fast_path ... ok
[INFO] [stdout] test book::tests::test_book_simple_buy ... ok
[INFO] [stdout] test book::tests::test_book_sell_with_total_price ... ok
[INFO] [stdout] test book::tests::test_book_sell_with_gain ... ok
[INFO] [stdout] test book::tests::test_book_transactions_multiple ... ok
[INFO] [stdout] test book::tests::test_book_with_total_cost ... ok
[INFO] [stdout] test book::tests::test_book_zero_gain ... ok
[INFO] [stdout] test book::tests::test_book_total_cost_then_sell ... ok
[INFO] [stdout] test book::tests::test_booking_engine_with_method ... ok
[INFO] [stdout] test book::tests::test_cost_currency_inference_from_other_postings ... ok
[INFO] [stdout] test book::tests::test_cost_spec_currency_inference ... ok
[INFO] [stdout] test book::tests::test_multi_posting_crosses_lot_boundary ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_balanced_with_cost_no_interpolation_needed ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_balanced_cost_removes_zero_posting ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_cost_currency_inferred_from_other_posting ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_cost_scale_preserved ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_cost_currency_inferred_elided_cash ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_error_multiple_missing_same_currency ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_multi_currency_three_currencies ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_negative_cost_units_sale ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_no_missing ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_multiple_postings ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_simple ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_stock_purchase_with_commission ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_uses_max_scale ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_rounds_to_quantum ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_multi_currency_single_elided ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_stock_sale_with_cost_and_price ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_multiple_currencies ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_zero_cost_removes_zero_posting ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_with_total_cost ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_with_per_unit_cost ... ok
[INFO] [stdout] test interpolate::tests::test_interpolate_zero_total_cost_removes_zero_posting ... ok
[INFO] [stdout] test pad::tests::test_merge_with_padding ... ok
[INFO] [stdout] test pad::tests::test_padding_transaction_has_p_flag ... ok
[INFO] [stdout] test pad::tests::test_process_pads_basic ... ok
[INFO] [stdout] test pad::tests::test_process_pads_multiple_currencies ... ok
[INFO] [stdout] test pad::tests::test_expand_pads ... ok
[INFO] [stdout] test pad::tests::test_process_pads_negative_adjustment ... ok
[INFO] [stdout] test pad::tests::test_process_pads_with_existing_balance ... ok
[INFO] [stdout] test tests::test_calculate_residual_explicit_cost_currency_takes_precedence ... ok
[INFO] [stdout] test tests::test_calculate_residual_infers_cost_currency_from_other_posting ... ok
[INFO] [stdout] test pad::tests::test_process_pads_no_difference ... ok
[INFO] [stdout] test tests::test_calculate_residual_cost_without_amount_skips ... ok
[INFO] [stdout] test tests::test_calculate_residual_infers_cost_currency_total_cost ... ok
[INFO] [stdout] test tests::test_calculate_residual_multi_currency_with_cost ... ok
[INFO] [stdout] test tests::test_calculate_residual_skips_incomplete_units ... ok
[INFO] [stdout] test tests::test_calculate_residual_total_empty_fallback ... ok
[INFO] [stdout] test pad::tests::test_process_pads_transaction_after_balance_ends_pad ... ok
[INFO] [stdout] test tests::test_calculate_residual_mixed_cost_and_simple ... ok
[INFO] [stdout] test tests::test_calculate_residual_balanced ... ok
[INFO] [stdout] test pad::tests::test_process_pads_unused_pad ... ok
[INFO] [stdout] test tests::test_calculate_residual_price_annotation_takes_precedence ... ok
[INFO] [stdout] test tests::test_calculate_residual_sell_with_gains ... ok
[INFO] [stdout] test tests::test_calculate_residual_total_incomplete_with_amount ... ok
[INFO] [stdout] test tests::test_calculate_residual_unit_incomplete_no_amount_fallback ... ok
[INFO] [stdout] test tests::test_calculate_residual_total_incomplete_no_amount_fallback ... ok
[INFO] [stdout] test tests::test_calculate_residual_with_per_unit_cost ... ok
[INFO] [stdout] test tests::test_calculate_residual_unit_incomplete_with_amount ... ok
[INFO] [stdout] test tests::test_calculate_residual_with_total_cost ... ok
[INFO] [stdout] test tests::test_calculate_residual_with_total_cost_negative_units ... ok
[INFO] [stdout] test tests::test_calculate_tolerance ... ok
[INFO] [stdout] test tests::test_infer_cost_currency_simple_takes_precedence ... ok
[INFO] [stdout] test tests::test_infer_cost_currency_zero_cost ... ok
[INFO] [stdout] test tests::test_is_balanced ... ok
[INFO] [stdout] test tests::test_is_balanced_within_tolerance ... ok
[INFO] [stdout] test tests::test_calculate_residual_with_total_price ... ok
[INFO] [stdout] test tests::test_calculate_residual_with_unit_price ... ok
[INFO] [stdout] test tests::test_calculate_residual_unbalanced ... ok
[INFO] [stdout] test tests::test_calculate_residual_with_unit_price_positive ... ok
[INFO] [stdout] test tests::test_calculate_residual_unit_empty_fallback ... ok
[INFO] [stdout] test tests::test_infer_cost_currency_from_cost_spec ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 74 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/tla_proptest.rs (/opt/rustwide/target/debug/deps/tla_proptest-c975523707988e32)
[INFO] [stdout] 
[INFO] [stdout] running 8 tests
[INFO] [stdout] test prop_complete_transaction_unchanged ... ok
[INFO] [stdout] test prop_interpolation_completes_balanced ... ok
[INFO] [stdout] test prop_interpolation_fills_correct_postings ... ok
[INFO] [stdout] test prop_zero_amount_interpolation ... ok
[INFO] [stdout] test prop_interpolation_preserves_explicit_amounts ... ok
[INFO] [stdout] test prop_interpolation_at_most_one_null_enforced ... ok
[INFO] [stdout] test prop_residual_is_deterministic ... ok
[INFO] [stdout] test prop_multi_currency_interpolation ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.01s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests rustledger_booking
[INFO] [stdout] 
[INFO] [stdout] running 2 tests
[INFO] [stdout] test src/interpolate.rs - interpolate::interpolate (line 94) ... ignored
[INFO] [stdout] test src/lib.rs - (line 13) ... ignored
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 2 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.27s; merged doctests compilation took 0.26s
[INFO] running `Command { std: "docker" "inspect" "2df29c083682d2cadbf753feccafb4e01ce15cc9c16db3ff3ce578769e9723da", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2df29c083682d2cadbf753feccafb4e01ce15cc9c16db3ff3ce578769e9723da", kill_on_drop: false }`
[INFO] [stdout] 2df29c083682d2cadbf753feccafb4e01ce15cc9c16db3ff3ce578769e9723da
